Dec 02 12:52:43.893 INFO testing tuf-0.3.0-alpha3 against master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61 for beta-1.31-5
Dec 02 12:52:43.893 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-6/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 12:52:44.316 INFO [stdout] 73f576ff3396b7bec3d8cd3a8a13b442dc2b85e8abb99c819583fec58e14ce18
Dec 02 12:52:44.318 INFO running `"docker" "start" "-a" "73f576ff3396b7bec3d8cd3a8a13b442dc2b85e8abb99c819583fec58e14ce18"`
Dec 02 12:52:45.619 INFO [stderr] usermod: no changes
Dec 02 12:52:45.839 INFO [stderr]    Compiling derp v0.0.4
Dec 02 12:52:45.839 INFO [stderr]    Compiling ring v0.11.0
Dec 02 12:52:58.611 INFO [stderr]    Compiling tuf v0.3.0-alpha3 (/source)
Dec 02 12:53:07.928 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 22.27s
Dec 02 12:53:07.938 INFO [stderr] su: No module specific data is present
Dec 02 12:53:09.015 INFO running `"docker" "inspect" "73f576ff3396b7bec3d8cd3a8a13b442dc2b85e8abb99c819583fec58e14ce18"`
Dec 02 12:53:09.287 INFO running `"docker" "rm" "-f" "73f576ff3396b7bec3d8cd3a8a13b442dc2b85e8abb99c819583fec58e14ce18"`
Dec 02 12:53:09.607 INFO [stdout] 73f576ff3396b7bec3d8cd3a8a13b442dc2b85e8abb99c819583fec58e14ce18
Dec 02 12:53:09.613 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-6/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 12:53:10.152 INFO [stdout] f750ccc0888f8985912dd9991ed813b5d08665f83eb7d7a60c53ccb5e60ecdee
Dec 02 12:53:10.156 INFO running `"docker" "start" "-a" "f750ccc0888f8985912dd9991ed813b5d08665f83eb7d7a60c53ccb5e60ecdee"`
Dec 02 12:53:11.439 INFO [stderr] usermod: no changes
Dec 02 12:53:11.635 INFO [stderr]    Compiling maplit v0.1.6
Dec 02 12:53:12.347 INFO [stderr]    Compiling tuf v0.3.0-alpha3 (/source)
Dec 02 12:53:43.287 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 31.82s
Dec 02 12:53:43.299 INFO [stderr] su: No module specific data is present
Dec 02 12:53:44.095 INFO running `"docker" "inspect" "f750ccc0888f8985912dd9991ed813b5d08665f83eb7d7a60c53ccb5e60ecdee"`
Dec 02 12:53:44.372 INFO running `"docker" "rm" "-f" "f750ccc0888f8985912dd9991ed813b5d08665f83eb7d7a60c53ccb5e60ecdee"`
Dec 02 12:53:44.563 INFO [stdout] f750ccc0888f8985912dd9991ed813b5d08665f83eb7d7a60c53ccb5e60ecdee
Dec 02 12:53:44.569 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-6/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 12:53:44.983 INFO [stdout] ddf4b65aa1925d044afc9ce354a27bd56ac7473affd58e6b9e0f3e3d05e61fb6
Dec 02 12:53:44.991 INFO running `"docker" "start" "-a" "ddf4b65aa1925d044afc9ce354a27bd56ac7473affd58e6b9e0f3e3d05e61fb6"`
Dec 02 12:53:45.848 INFO [stderr] usermod: no changes
Dec 02 12:53:46.017 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Dec 02 12:53:46.039 INFO [stderr]      Running /target/debug/deps/tuf-3d04be68e56b88ee
Dec 02 12:53:46.042 INFO [stdout] 
Dec 02 12:53:46.042 INFO [stdout] running 68 tests
Dec 02 12:53:46.055 INFO [stdout] test crypto::test::parse_rsa_4096_spki ... ok
Dec 02 12:53:46.057 INFO [stdout] test crypto::test::ed25519_read_pkcs8_and_sign ... ok
Dec 02 12:53:46.057 INFO [stdout] test crypto::test::parse_rsa_2048_spki ... ok
Dec 02 12:53:46.057 INFO [stdout] test crypto::test::extract_pkcs1_from_rsa_4096_pkcs8 ... ok
Dec 02 12:53:46.058 INFO [stdout] test crypto::test::extract_pkcs1_from_rsa_2048_pkcs8 ... ok
Dec 02 12:53:46.067 INFO [stdout] test crypto::test::serde_signature_value ... ok
Dec 02 12:53:46.068 INFO [stdout] test crypto::test::serde_key_id ... ok
Dec 02 12:53:46.069 INFO [stdout] test crypto::test::serde_rsa_public_key ... ok
Dec 02 12:53:46.070 INFO [stdout] test crypto::test::serde_signature ... ok
Dec 02 12:53:46.070 INFO [stdout] test crypto::test::serde_ed25519_public_key ... ok
Dec 02 12:53:46.071 INFO [stdout] test interchange::cjson::test::write_obj ... ok
Dec 02 12:53:46.071 INFO [stdout] test interchange::cjson::test::write_arr ... ok
Dec 02 12:53:46.071 INFO [stdout] test metadata::test::deserialize_json_delegation_bad_threshold ... ok
Dec 02 12:53:46.071 INFO [stdout] test interchange::cjson::test::write_str ... ok
Dec 02 12:53:46.081 INFO [stdout] test metadata::test::deserialize_json_delegation_duplicate_key_ids ... ok
Dec 02 12:53:46.081 INFO [stdout] test metadata::test::deserialize_json_delegation_duplicate_paths ... ok
Dec 02 12:53:46.094 INFO [stdout] test metadata::test::deserialize_json_delegations_no_keys ... ok
Dec 02 12:53:46.095 INFO [stdout] test metadata::test::deserialize_json_delegations_no_roles ... ok
Dec 02 12:53:46.095 INFO [stdout] test metadata::test::deserialize_json_role_definition_duplicate_key_ids ... ok
Dec 02 12:53:46.095 INFO [stdout] test metadata::test::deserialize_json_delegations_duplicate_keys ... ok
Dec 02 12:53:46.095 INFO [stdout] test metadata::test::deserialize_json_delegations_duplicated_roles ... ok
Dec 02 12:53:46.100 INFO [stdout] test metadata::test::deserialize_json_role_definition_illegal_threshold ... ok
Dec 02 12:53:46.101 INFO [stdout] test metadata::test::deserialize_json_snapshot_bad_type ... ok
Dec 02 12:53:46.104 INFO [stdout] test metadata::test::deserialize_json_root_duplicate_keys ... ok
Dec 02 12:53:46.107 INFO [stdout] test crypto::test::rsa_2048_read_pkcs8_and_sign ... ok
Dec 02 12:53:46.109 INFO [stdout] test metadata::test::deserialize_json_targets_illegal_version ... ok
Dec 02 12:53:46.109 INFO [stdout] test metadata::test::deserialize_json_snapshot_illegal_version ... ok
Dec 02 12:53:46.109 INFO [stdout] test metadata::test::deserialize_json_root_bad_type ... ok
Dec 02 12:53:46.110 INFO [stdout] test metadata::test::deserialize_json_targets_bad_type ... ok
Dec 02 12:53:46.111 INFO [stdout] test metadata::test::serde_role_definition ... ok
Dec 02 12:53:46.111 INFO [stdout] test metadata::test::deserialize_json_timestamp_illegal_version ... ok
Dec 02 12:53:46.112 INFO [stdout] test metadata::test::serde_metadata_path ... ok
Dec 02 12:53:46.112 INFO [stdout] test metadata::test::path_matches_chain ... ok
Dec 02 12:53:46.117 INFO [stdout] test client::test::root_chain_update ... ok
Dec 02 12:53:46.117 INFO [stdout] test metadata::test::serde_snapshot_metadata ... ok
Dec 02 12:53:46.131 INFO [stdout] test metadata::test::serde_target_path ... ok
Dec 02 12:53:46.131 INFO [stdout] test metadata::test::serde_targets_metadata ... ok
Dec 02 12:53:46.131 INFO [stdout] test metadata::test::serde_root_metadata ... ok
Dec 02 12:53:46.131 INFO [stdout] test metadata::test::deserialize_json_timestamp_bad_type ... ok
Dec 02 12:53:46.131 INFO [stdout] test metadata::test::serde_target_description ... ok
Dec 02 12:53:46.131 INFO [stdout] test metadata::test::deserialize_json_root_illegal_version ... ok
Dec 02 12:53:46.142 INFO [stdout] test metadata::test::serde_targets_with_delegations_metadata ... ok
Dec 02 12:53:46.142 INFO [stdout] test metadata::test::serde_timestamp_metadata ... ok
Dec 02 12:53:46.143 INFO [stdout] test repository::test::ephemeral_repo_targets ... ok
Dec 02 12:53:46.143 INFO [stdout] test metadata::test::serde_signed_metadata ... ok
Dec 02 12:53:46.165 INFO [stdout] test tuf::test::bad_timestamp_update_wrong_key ... ok
Dec 02 12:53:46.175 INFO [stdout] test tuf::test::bad_targets_update_wrong_key ... ok
Dec 02 12:53:46.175 INFO [stdout] test tuf::test::good_snapshot_update ... ok
Dec 02 12:53:46.192 INFO [stdout] test repository::test::file_system_repo_targets ... ok
Dec 02 12:53:46.192 INFO [stdout] test tuf::test::bad_targets_update_wrong_version ... ok
Dec 02 12:53:46.196 INFO [stdout] test tuf::test::bad_snapshot_update_wrong_version ... ok
Dec 02 12:53:46.196 INFO [stdout] test tuf::test::no_cross_sign_root_rotation ... ok
Dec 02 12:53:46.196 INFO [stdout] test tuf::test::bad_snapshot_update_wrong_key ... ok
Dec 02 12:53:46.212 INFO [stdout] test tuf::test::root_pinned_failure ... ok
Dec 02 12:53:46.212 INFO [stdout] test tuf::test::good_root_rotation ... ok
Dec 02 12:53:46.212 INFO [stdout] test tuf::test::root_pinned_success ... ok
Dec 02 12:53:46.212 INFO [stdout] test tuf::test::good_timestamp_update ... ok
Dec 02 12:53:46.212 INFO [stdout] test tuf::test::good_targets_update ... ok
Dec 02 12:53:46.212 INFO [stdout] test util::test::invalid_read_above_max_size_large_data ... ok
Dec 02 12:53:46.212 INFO [stdout] test util::test::invalid_read_above_max_size ... ok
Dec 02 12:53:46.212 INFO [stdout] test util::test::valid_read_good_hash ... ok
Dec 02 12:53:46.212 INFO [stdout] test util::test::valid_read_large_data ... ok
Dec 02 12:53:46.212 INFO [stdout] test util::test::invalid_read_bad_hash_large_data ... ok
Dec 02 12:53:46.212 INFO [stdout] test util::test::valid_read_good_hash_large_data ... ok
Dec 02 12:53:46.212 INFO [stdout] test util::test::invalid_read_bad_hash ... ok
Dec 02 12:53:46.215 INFO [stdout] test util::test::valid_read_below_max_size ... ok
Dec 02 12:53:46.215 INFO [stdout] test util::test::valid_read ... ok
Dec 02 12:53:46.355 INFO [stdout] test crypto::test::rsa_4096_read_pkcs8_and_sign ... ok
Dec 02 12:53:46.355 INFO [stdout] 
Dec 02 12:53:46.355 INFO [stdout] test result: ok. 68 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 12:53:46.355 INFO [stdout] 
Dec 02 12:53:46.359 INFO [stdout] 
Dec 02 12:53:46.359 INFO [stderr]      Running /target/debug/deps/integration-b52d34e878a6a2d2
Dec 02 12:53:46.359 INFO [stdout] running 2 tests
Dec 02 12:53:46.399 INFO [stdout] test nested_delegation ... ok
Dec 02 12:53:46.407 INFO [stdout] test simple_delegation ... ok
Dec 02 12:53:46.407 INFO [stdout] 
Dec 02 12:53:46.407 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 12:53:46.407 INFO [stdout] 
Dec 02 12:53:46.407 INFO [stdout] 
Dec 02 12:53:46.407 INFO [stdout] running 2 tests
Dec 02 12:53:46.407 INFO [stderr]      Running /target/debug/deps/simple_example-0f772885d88bd240
Dec 02 12:53:46.479 INFO [stdout] test with_translator ... ok
Dec 02 12:53:46.479 INFO [stdout] test without_translator ... ok
Dec 02 12:53:46.479 INFO [stdout] 
Dec 02 12:53:46.479 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 12:53:46.479 INFO [stdout] 
Dec 02 12:53:46.483 INFO [stderr]    Doc-tests tuf
Dec 02 12:53:50.807 INFO [stdout] 
Dec 02 12:53:50.807 INFO [stdout] running 24 tests
Dec 02 12:53:58.287 INFO [stdout] test src/crypto.rs - crypto::PrivateKey::from_pkcs8 (line 355) ... ok
Dec 02 12:54:27.661 INFO [stdout] test src/client.rs - client (line 5) ... ok
Dec 02 12:54:31.913 INFO [stdout] test src/interchange/mod.rs - interchange::Json::extension (line 224) ... ok
Dec 02 12:54:32.701 INFO [stdout] test src/interchange/mod.rs - interchange::Json::deserialize (line 244) ... ok
Dec 02 12:54:33.091 INFO [stdout] test src/interchange/mod.rs - interchange::Json::canonicalize (line 232) ... ok
Dec 02 12:54:35.483 INFO [stdout] test src/crypto.rs - crypto::hash_preference (line 37) ... ok
Dec 02 12:54:36.483 INFO [stdout] test src/client.rs - client::Config (line 628) ... ok
Dec 02 12:54:37.211 INFO [stdout] test src/client.rs - client::PathTranslator (line 68) ... ok
Dec 02 12:54:47.539 INFO [stdout] test src/interchange/mod.rs - interchange::Json::from_reader (line 319) ... ok
Dec 02 12:55:08.387 INFO [stdout] test src/interchange/mod.rs - interchange::Json::serialize (line 273) ... ok
Dec 02 12:55:15.351 INFO [stdout] test src/interchange/mod.rs - interchange::Json::to_writer (line 302) ... ok
Dec 02 12:55:19.903 INFO [stdout] test src/metadata.rs - metadata::MetadataPath (line 677) ... ok
Dec 02 12:55:23.866 INFO [stdout] test src/metadata.rs - metadata::MetadataPath::components (line 728) ... ok
Dec 02 12:55:24.795 INFO [stdout] test src/metadata.rs - metadata::MetadataPath::from_role (line 710) ... ok
Dec 02 12:55:25.223 INFO [stdout] test src/metadata.rs - metadata::MetadataPath::new (line 692) ... ok
Dec 02 12:55:27.967 INFO [stdout] test src/metadata.rs - metadata::Role::fuzzy_matches_path (line 159) ... ok
Dec 02 12:55:39.735 INFO [stdout] test src/metadata.rs - metadata::SignedMetadata<D, M>::add_signature (line 287) ... ok
Dec 02 12:55:54.865 INFO [stdout] test src/metadata.rs - metadata::SignedMetadata<D, M>::new (line 244) ... ok
Dec 02 12:56:01.415 INFO [stdout] test src/metadata.rs - metadata::SignedMetadata<D, M>::verify (line 375) ... ok
Dec 02 12:56:05.959 INFO [stdout] test src/metadata.rs - metadata::TargetDescription::from_reader (line 1162) ... ok
Dec 02 12:56:07.271 INFO [stdout] test src/metadata.rs - metadata::VirtualTargetPath::components (line 1022) ... ok
Dec 02 12:56:08.243 INFO [stdout] test src/metadata.rs - metadata::TargetPath::components (line 1120) ... ok
Dec 02 12:56:08.259 INFO [stdout] test src/metadata.rs - metadata::VirtualTargetPath::is_child (line 1033) ... ok
Dec 02 12:56:08.259 INFO [stdout] test src/metadata.rs - metadata::VirtualTargetPath::new (line 1003) ... ok
Dec 02 12:56:08.259 INFO [stdout] 
Dec 02 12:56:08.260 INFO [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 12:56:08.260 INFO [stdout] 
Dec 02 12:56:08.282 INFO [stderr] su: No module specific data is present
Dec 02 12:56:09.568 INFO running `"docker" "inspect" "ddf4b65aa1925d044afc9ce354a27bd56ac7473affd58e6b9e0f3e3d05e61fb6"`
Dec 02 12:56:09.827 INFO running `"docker" "rm" "-f" "ddf4b65aa1925d044afc9ce354a27bd56ac7473affd58e6b9e0f3e3d05e61fb6"`
Dec 02 12:56:10.094 INFO [stdout] ddf4b65aa1925d044afc9ce354a27bd56ac7473affd58e6b9e0f3e3d05e61fb6
